Re: Bootup regression introduced by7bd0b0f0da3b1ec11cbcc798eb0ef747a1184077 ("memblock: Reimplement memblockallocation using reverse free area iterato") in v3.3-rc0

From: Konrad Rzeszutek Wilk
Date: Wed Jan 11 2012 - 15:06:39 EST


On Tue, Jan 10, 2012 at 03:15:52PM -0800, Tejun Heo wrote:
> Hello,
>
> On Tue, Jan 10, 2012 at 05:45:37PM -0500, Konrad Rzeszutek Wilk wrote:
> > (early) [ 0.000000] memblock_find: [0x0, 0xfcdd000) size=8409088 align=4096 nid=1024
> > (early) [ 0.000000] memblock_find: [0x805000, 0xfcdd000) - adjusted
> > (early) [ 0.000000] memblock_find: cand [0x10567000, 0x100000000) -> (early) [0xfcdd000, 0xfcdd000) (early) - rejected
> > (early) [ 0.000000] memblock_find: cand [0x1e03000, 0x220a000) -> (early) [0x1e03000, 0x220a000) (early) - rejected
> > (early) [ 0.000000] memblock_find: cand [0x100000, 0x1000000) -> (early) [0x805000, 0x1000000) (early) - rejected
> > (early) [ 0.000000] memblock_find: cand [0x10000, 0x9b000) -> (early) [0x805000, 0x805000) (early) - rejected
> > (early) [ 0.000000] Kernel panic - not syncing: Cannot find space for the kernel page tables
>
> So, it actually is a legitimate alloc failure. It seems I've tried a
> bit too hard at simplifying the allocator. Does the following fix the
> problem?
>
> Thanks.
>
> diff --git a/mm/memblock.c b/mm/memblock.c
> index 2f55f19..77b5f22 100644
> --- a/mm/memblock.c
> +++ b/mm/memblock.c
> @@ -106,14 +106,17 @@ phys_addr_t __init_memblock memblock_find_in_range_node(phys_addr_t start,
> if (end == MEMBLOCK_ALLOC_ACCESSIBLE)
> end = memblock.current_limit;
>
> - /* adjust @start to avoid underflow and allocating the first page */
> - start = max3(start, size, (phys_addr_t)PAGE_SIZE);
> + /* avoid allocating the first page */
> + start = max_t(phys_addr_t, start, PAGE_SIZE);
> end = max(start, end);
>
> for_each_free_mem_range_reverse(i, nid, &this_start, &this_end, NULL) {
> this_start = clamp(this_start, start, end);
> this_end = clamp(this_end, start, end);
>
> + if (this_end < size)
> + continue;
> +
> cand = round_down(this_end - size, align);
> if (cand >= this_start)
> return cand;

With that patch it boots!


(early) [ 0.000000] Initializing cgroup subsys cpuset
(early) [ 0.000000] Initializing cgroup subsys cpu
(early) [ 0.000000] Linux version 3.2.0-05693-g2c81411 (konrad@xxxxxxxxxxxxxxxxxxx) (gcc version 4.4.4 20100503 (Red Hat 4.4.4-2) (GCC) ) #1 SMP PREEMPT Wed Jan 11 13:19:30 EST 2012
(early) [ 0.000000] Command line: console=hvc0 debug earlyprintk=xen
(early) [ 0.000000] ACPI in unprivileged domain disabled
(early) [ 0.000000] Released 0 pages of unused memory
(early) [ 0.000000] Set 0 page(s) to 1-1 mapping
(early) [ 0.000000] BIOS-provided physical RAM map:
(early) [ 0.000000] Xen: 0000000000000000 - 00000000000a0000 (usable)
(early) [ 0.000000] Xen: 00000000000a0000 - 0000000000100000 (reserved)
(early) [ 0.000000] Xen: 0000000000100000 - 0000000200800000 (usable)
(early) [ 0.000000] bootconsole [xenboot0] enabled
(early) [ 0.000000] NX (Execute Disable) protection: active
(early) [ 0.000000] DMI not present or invalid.
(early) [ 0.000000] e820 update range: 0000000000000000 - 0000000000010000 (early) (usable)(early) ==> (early) (reserved)(early)
(early) [ 0.000000] e820 remove range: 00000000000a0000 - 0000000000100000 (early) (usable)(early)
(early) [ 0.000000] No AGP bridge found
(early) [ 0.000000] last_pfn = 0x200800 max_arch_pfn = 0x400000000
(early) [ 0.000000] last_pfn = 0x100000 max_arch_pfn = 0x400000000
(early) [ 0.000000] initial memory mapped : 0 - 10006000
(early) [ 0.000000] Base memory trampoline at [ffff88000009b000] 9b000 size 20480
(early) [ 0.000000] init_memory_mapping: 0000000000000000-0000000100000000
(early) [ 0.000000] 0000000000 - 0100000000 page 4k
(early) [ 0.000000] kernel direct mapping tables up to 100000000 @ 7fb000-1000000
(early) [ 0.000000] xen: setting RW the range f74000 - 1000000
(early) [ 0.000000] init_memory_mapping: 0000000100000000-0000000200800000
(early) [ 0.000000] 0100000000 - 0200800000 page 4k
(early) [ 0.000000] kernel direct mapping tables up to 200800000 @ feff2000-100000000
(early) [ 0.000000] xen: setting RW the range ff7fb000 - 100000000
(early) [ 0.000000] RAMDISK: 02249000 - 10006000
(early) [ 0.000000] No NUMA configuration found
(early) [ 0.000000] Faking a node at 0000000000000000-0000000200800000
(early) [ 0.000000] Initmem setup node 0 0000000000000000-0000000200800000
(early) [ 0.000000] NODE_DATA [00000000fffd9000 - 00000000ffffffff]
(early) [ 0.000000] Zone PFN ranges:
(early) [ 0.000000] DMA (early) 0x00000010 -> 0x00001000
(early) [ 0.000000] DMA32 (early) 0x00001000 -> 0x00100000
(early) [ 0.000000] Normal (early) 0x00100000 -> 0x00200800
(early) [ 0.000000] Movable zone start PFN for each node
(early) [ 0.000000] Early memory PFN ranges
(early) [ 0.000000] 0: 0x00000010 -> 0x000000a0
(early) [ 0.000000] 0: 0x00000100 -> 0x00200800
(early) [ 0.000000] On node 0 totalpages: 2099088
(early) [ 0.000000] DMA zone: 64 pages used for memmap
(early) [ 0.000000] DMA zone: 1918 pages reserved
(early) [ 0.000000] DMA zone: 2002 pages, LIFO batch:0
(early) [ 0.000000] DMA32 zone: 16320 pages used for memmap
(early) [ 0.000000] DMA32 zone: 1028160 pages, LIFO batch:31
(early) [ 0.000000] Normal zone: 16416 pages used for memmap
(early) [ 0.000000] Normal zone: 1034208 pages, LIFO batch:31
(early) [ 0.000000] SMP: Allowing 4 CPUs, 0 hotplug CPUs
(early) [ 0.000000] No local APIC present
(early) [ 0.000000] APIC: disable apic facility
(early) [ 0.000000] APIC: switched to apic NOOP
(early) [ 0.000000] nr_irqs_gsi: 16
(early) [ 0.000000] PM: Registered nosave memory: 00000000000a0000 - 0000000000100000
(early) [ 0.000000] PCI: Warning: Cannot find a gap in the 32bit address range
(early) [ 0.000000] PCI: Unassigned devices with 32bit resource registers may break!
(early) [ 0.000000] Allocating PCI resources starting at 200900000 (gap: 200900000:400000)
(early) [ 0.000000] Booting paravirtualized kernel on Xen
(early) [ 0.000000] Xen version: 4.1-120111 (preserve-AD)
(early) [ 0.000000] setup_percpu: NR_CPUS:4096 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1
(early) [ 0.000000] PERCPU: Embedded 28 pages/cpu @ffff8800fff31000 s82752 r8192 d23744 u114688
(early) [ 0.000000] pcpu-alloc: s82752 r8192 d23744 u114688 alloc=28*4096(early)
(early) [ 0.000000] pcpu-alloc: (early) [0] (early) 0 (early) [0] (early) 1 (early) [0] (early) 2 (early) [0] (early) 3 (early)
(early) [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 2064370
(early) [ 0.000000] Policy zone: Normal
(early) [ 0.000000] Kernel command line: console=hvc0 debug earlyprintk=xen
(early) [ 0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes)
(early) [ 0.000000] Checking aperture...
(early) [ 0.000000] No AGP bridge found
(early) [ 0.000000] Calgary: detecting Calgary via BIOS EBDA area
(early) [ 0.000000] Calgary: Unable to locate Rio Grande table in EBDA - bailing!
(early) [ 0.000000] Memory: 3727344k/8396800k available (6482k kernel code, 448k absent, 4669008k reserved, 4624k data, 1256k init)
(early) [ 0.000000] SLUB: Genslabs=15, HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
(early) [ 0.000000] Preemptible hierarchical RCU implementation.
(early) [ 0.000000] NR_IRQS:262400 nr_irqs:304 16
(early) [ 0.000000] kmemleak: Early log buffer exceeded, please increase DEBUG_KMEMLEAK_EARLY_LOG_SIZE
(early) [ 0.000000] kmemleak: Kernel memory leak detector disabled
(early) [ 0.000000] Console: colour dummy device 80x25
(early) [ 0.000000] console [tty0] enabled
[ 0.000000] console [hvc0] enabled, bootconsole disabled
(early) [ 0.000000] console [hvc0] enabled, bootconsole disabled
[ 0.000000] Xen: using vcpuop timer interface
[ 0.000000] installing Xen timer for CPU 0
[ 0.000000] Detected 3292.616 MHz processor.
[ 0.000999] Calibrating delay loop (skipped), value calculated using timer frequency.. 6585.23 BogoMIPS (lpj=3292616)
[ 0.000999] pid_max: default: 32768 minimum: 301
[ 0.000999] Security Framework initialized
[ 0.000999] SELinux: Initializing.
[ 0.000999] SELinux: Starting in permissive mode
[ 0.002170] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes)
[ 0.004675] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes)
[ 0.005213] Mount-cache hash table entries: 256
[ 0.005428] Initializing cgroup subsys cpuacct
[ 0.005436] Initializing cgroup subsys freezer
[ 0.005497] ENERGY_PERF_BIAS: Set to 'normal', was 'performance'
[ 0.005498] ENERGY_PERF_BIAS: View and update with x86_energy_perf_policy(8)
[ 0.005510] CPU: Physical Processor ID: 0
[ 0.005515] CPU: Processor Core ID: 0
[ 0.005576] SMP alternatives: switching to UP code
[ 0.005999] ftrace: allocating 23453 entries in 92 pages
[ 0.006057] cpu 0 spinlock event irq 17
[ 0.006112] Performance Events: unsupported p6 CPU model 42 no PMU driver, software events only.
[ 0.012038] NMI watchdog disabled (cpu0): hardware events not enabled
[ 0.018010] installing Xen timer for CPU 1
[ 0.018028] cpu 1 spinlock event irq 23
[ 0.018051] SMP alternatives: switching to SMP code
[ 0.019085] NMI watchdog disabled (cpu1): hardware events not enabled
[ 0.025009] installing Xen timer for CPU 2
[ 0.025027] cpu 2 spinlock event irq 29
[ 0.025121] NMI watchdog disabled (cpu2): hardware events not enabled
[ 0.031008] installing Xen timer for CPU 3
[ 0.031024] cpu 3 spinlock event irq 35
[ 0.031118] NMI watchdog disabled (cpu3): hardware events not enabled
[ 0.033006] Brought up 4 CPUs
[ 0.033666] kworker/u:0 used greatest stack depth: 5272 bytes left
[ 0.033666] Grant tables using version 2 layout.
[ 0.033666] Grant table initialized
[ 0.052849] RTC time: 165:165:165, date: 165/165/65
[ 0.053033] NET: Registered protocol family 16
[ 0.054556] PCI: setting up Xen PCI frontend stub
[ 0.054565] PCI: pci_cache_line_size set to 64 bytes
[ 0.065198] bio: create slab <bio-0> at 0
[ 0.065198] ACPI: Interpreter disabled.
[ 0.066004] xen/balloon: Initialising balloon driver.
[ 0.076187] xen-balloon: Initialising balloon driver.
[ 0.076187] vgaarb: loaded
[ 0.077064] usbcore: registered new interface driver usbfs
[ 0.077067] usbcore: registered new interface driver hub
[ 0.077107] usbcore: registered new device driver usb
[ 0.077107] PCI: System does not support PCI
[ 0.077107] PCI: System does not support PCI
[ 0.078054] NetLabel: Initializing
[ 0.078054] NetLabel: domain hash size = 128
[ 0.078054] NetLabel: protocols = UNLABELED CIPSOv4
[ 0.078054] NetLabel: unlabeled traffic allowed by default
[ 0.078109] Switching to clocksource xen
[ 0.083574] pnp: PnP ACPI: disabled
[ 0.089832] PCI: max bus depth: 0 pci_try_num: 1
[ 0.089877] NET: Registered protocol family 2
[ 0.090665] IP route cache hash table entries: 262144 (order: 9, 2097152 bytes)
[ 0.093957] TCP established hash table entries: 524288 (order: 11, 8388608 bytes)
[ 0.095324] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes)
[ 0.095466] TCP: Hash tables configured (established 524288 bind 65536)
[ 0.095474] TCP reno registered
[ 0.095526] UDP hash table entries: 4096 (order: 5, 131072 bytes)
[ 0.095597] UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes)
[ 0.095720] NET: Registered protocol family 1
[ 0.095957] RPC: Registered named UNIX socket transport module.
[ 0.095965] RPC: Registered udp transport module.
[ 0.095970] RPC: Registered tcp transport module.
[ 0.095976] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 0.095984] PCI: CLS 0 bytes, default 64
[ 0.096219] Trying to unpack rootfs image as initramfs...
[ 0.431565] Freeing initrd memory: 227060k freed
[ 0.475737] DMA-API: preallocated 32768 debug entries
[ 0.475961] DMA-API: debugging enabled by kernel config
[ 0.475969] PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
[ 0.475977] Placing 64MB software IO TLB between ffff8800f2800000 - ffff8800f6800000
[ 0.475984] software IO TLB at phys 0xf2800000 - 0xf6800000
[ 0.476324] platform rtc_cmos: registered platform RTC device (no PNP device found)
[ 0.476472] Machine check injector initialized
[ 0.477452] microcode: CPU0 sig=0x206a7, pf=0x2, revision=0x17
[ 0.477466] microcode: CPU1 sig=0x206a7, pf=0x2, revision=0x17
[ 0.477486] microcode: CPU2 sig=0x206a7, pf=0x2, revision=0x17
[ 0.477503] microcode: CPU3 sig=0x206a7, pf=0x2, revision=0x17
[ 0.477586] microcode: Microcode Update Driver: v2.00 <tigran@xxxxxxxxxxxxxxxxxxxx>, Peter Oruba
[ 0.478032] audit: initializing netlink socket (disabled)
[ 0.478053] type=2000 audit(1326338469.110:1): initialized
[ 0.494006] HugeTLB registered 2 MB page size, pre-allocated 0 pages
[ 0.499995] VFS: Disk quotas dquot_6.5.2
[ 0.500208] Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[ 0.501045] NTFS driver 2.1.30 [Flags: R/W].
[ 0.501365] msgmni has been set to 7723
[ 0.501583] SELinux: Registering netfilter hooks
[ 0.502294] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253)
[ 0.502303] io scheduler noop registered
[ 0.502309] io scheduler deadline registered
[ 0.502405] io scheduler cfq registered (default)
[ 0.502633] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
[ 0.542586] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[ 0.573641] Non-volatile memory driver v1.3
[ 0.573649] Linux agpgart interface v0.103
[ 0.574083] [drm] Initialized drm 1.1.0 20060810
[ 0.577049] brd: module loaded
[ 0.578684] loop: module loaded
[ 0.579544] Fixed MDIO Bus: probed
[ 0.579551] tun: Universal TUN/TAP device driver, 1.6
[ 0.579556] tun: (C) 1999-2004 Max Krasnyansky <maxk@xxxxxxxxxxxx>
[ 0.580300] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 0.580308] ehci_hcd: block sizes: qh 112 qtd 96 itd 192 sitd 96
[ 0.580386] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[ 0.580392] ohci_hcd: block sizes: ed 80 td 96
[ 0.580466] uhci_hcd: USB Universal Host Controller Interface driver
[ 0.580701] usbcore: registered new interface driver usblp
[ 0.580780] usbcore: registered new interface driver libusual
[ 0.581039] i8042: PNP: No PS/2 controller found. Probing ports directly.
[ 0.581865] i8042: No controller found
[ 0.581951] mousedev: PS/2 mouse device common for all mice
[ 0.622367] rtc_cmos rtc_cmos: rtc core: registered rtc_cmos as rtc0
[ 0.622469] rtc_cmos: probe of rtc_cmos failed with error -38
[ 0.622730] EFI Variables Facility v0.08 2004-May-17
[ 0.622805] zram: num_devices not specified. Using default: 1
[ 0.622812] zram: Creating 1 devices ...
[ 0.623448] Netfilter messages via NETLINK v0.30.
[ 0.623467] nf_conntrack version 0.5.0 (16384 buckets, 65536 max)
[ 0.623780] ctnetlink v0.93: registering with nfnetlink.
[ 0.625065] ip_tables: (C) 2000-2006 Netfilter Core Team
[ 0.625099] TCP cubic registered
[ 0.625105] Initializing XFRM netlink socket
[ 0.625468] NET: Registered protocol family 10
[ 0.627394] ip6_tables: (C) 2000-2006 Netfilter Core Team
[ 0.627485] IPv6 over IPv4 tunneling driver
[ 0.629062] NET: Registered protocol family 17
[ 0.629097] Registering the dns_resolver key type
[ 0.629362] PM: Hibernation image not present or could not be loaded.
[ 0.629386] registered taskstats version 1
[ 0.629448] XENBUS: Device with no driver: device/vif/0
[ 0.629454] XENBUS: Device with no driver: device/vfb/0
[ 0.629460] XENBUS: Device with no driver: device/vkbd/0
[ 0.629475] Magic number: 1:252:3141
[ 0.630415] Freeing unused kernel memory: 1256k freed
[ 0.630622] Write protecting the kernel read-only data: 10240k
[ 0.636139] Freeing unused kernel memory: 1688k freed
[ 0.636508] Freeing unused kernel memory: 112k freed
init started: BusyBox v1.14.3 (2012-01-11 13:22:11 EST)
[ 0.641820] consoletype used greatest stack depth: 5232 bytes left
Mounting directories [ OK ]
[ 0.860513] modprobe used greatest stack depth: 5008 bytes left
mount: mount point /sys/kernel/config does not exist
[ 0.865846] core_filesystem used greatest stack depth: 4880 bytes left
[ 0.874814] input: Xen Virtual Keyboard as /devices/virtual/input/input0
[ 0.875019] input: Xen Virtual Pointer as /devices/virtual/input/input1
[ 1.086237] Initialising Xen virtual ethernet driver.
[ 1.201417] udevd (1186): /proc/1186/oom_adj is deprecated, please use /proc/1186/oom_score_adj instead.
udevd-work[1202]: error opening ATTR{/sys/devices/system/cpu/cpu0/online} for writing: No such file or directory

[ 1.307448] ip used greatest stack depth: 3696 bytes left
Waiting for devices [ OK ]
Waiting for fb [ OK ]
Starting..[/dev/fb0]
/dev/fb0: len:0
/dev/fb0: bits/pixel32
(7fa51499a000): Writting .. [800:600]
Done!
FATAL: Module agpgart_intel not found.
[ 1.464693] Console: switching to colour frame buffer device 100x37
[ 1.478942] [drm] radeon kernel modesetting enabled.
WARNING: Error inserting video (/lib/modules/3.2.0-05693-g2c81411/kernel/drivers/acpi/video.ko): No such device
WARNING: Error inserting mxm_wmi (/lib/modules/3.2.0-05693-g2c81411/kernel/drivers/platform/x86/mxm-wmi.ko): No such device
WARNING: Error inserting drm_kms_helper (/lib/modules/3.2.0-05693-g2c81411/kernel/drivers/gpu/drm/drm_kms_helper.ko): No such device
WARNING: Error inserting ttm (/lib/modules/3.2.0-05693-g2c81411/kernel/drivers/gpu/drm/ttm/ttm.ko): No such device
FATAL: Error inserting nouveau (/lib/modules/3.2.0-05693-g2c81411/kernel/drivers/gpu/drm/nouveau/nouveau.ko): No such device
WARNING: Error inserting drm_kms_helper (/lib/modules/3.2.0-05693-g2c81411/kernel/drivers/gpu/drm/drm_kms_helper.ko): No such device
FATAL: Error inserting i915 (/lib/modules/3.2.0-05693-g2c81411/kernel/drivers/gpu/drm/i915/i915.ko): No such device
Starting..[/dev/fb0]
/dev/fb0: len:0
/dev/fb0: bits/pixel32
(7fc2635c3000): Writting .. [800:600]
Done!
VGA: 0000:
Waiting for network [ OK ]
Bringing up loopback interface: [ OK ]
Bringing up interface eth0: [ 1.743980] device eth0 entered promiscuous mode
[ OK ]
Bringing up interface switch:
Determining IP information for switch...[ 1.790208] switch: port 1(eth0) entering forwarding state
[ 1.790244] switch: port 1(eth0) entering forwarding state
[ 1.790880] ip used greatest stack depth: 3376 bytes left
done.
[ OK ]
Waiting for init.custom [ OK ]

Starting SSHd ...

SSH started [2314]


Waiting for SSHd [ OK ]
WARNING: ssh currently running [2314] ignoring start request
FATAL: Module dump_dma not found.
ERROR: Module dump_dma does not exist in /proc/modules
[ 3.562254] SCSI subsystem initialized
[ 3.563911] Loading iSCSI transport class v2.0-870.
[ 3.566452] iscsi: registered transport (tcp)
iscsistart: transport class version 2.0-870. iscsid version 2.0-872
Could not get list of targets from firmware.
Jan 12 03:21:12 g-pvops syslogd 1.5.0: restart.
FATAL: Module evtchn not found.
[ 3.595640] Event-channel device installed.
xencommons should be started first.
CPU0 CPU1 CPU2 CPU3
16: 1330 0 0 0 xen-percpu-virq timer0
17: 6 0 0 0 xen-percpu-ipi spinlock0
18: 1872 0 0 0 xen-percpu-ipi resched0
19: 129 0 0 0 xen-percpu-ipi callfunc0
20: 0 0 0 0 xen-percpu-virq debug0
21: 77 0 0 0 xen-percpu-ipi callfuncsingle0
22: 0 1811 0 0 xen-percpu-virq timer1
23: 0 14 0 0 xen-percpu-ipi spinlock1
24: 0 2411 0 0 xen-percpu-ipi resched1
25: 0 140 0 0 xen-percpu-ipi callfunc1
26: 0 0 0 0 xen-percpu-virq debug1
27: 0 78 0 0 xen-percpu-ipi callfuncsingle1
28: 0 0 1204 0 xen-percpu-virq timer2
29: 0 0 5 0 xen-percpu-ipi spinlock2
30: 0 0 3713 0 xen-percpu-ipi resched2
31: 0 0 148 0 xen-percpu-ipi callfunc2
32: 0 0 0 0 xen-percpu-virq debug2
33: 0 0 103 0 xen-percpu-ipi callfuncsingle2
34: 0 0 0 1373 xen-percpu-virq timer3
35: 0 0 0 5 xen-percpu-ipi spinlock3
36: 0 0 0 2474 xen-percpu-ipi resched3
37: 0 0 0 131 xen-percpu-ipi callfunc3
38: 0 0 0 0 xen-percpu-virq debug3
39: 0 0 0 88 xen-percpu-ipi callfuncsingle3
40: 423 0 0 0 xen-dyn-event xenbus
41: 81 0 0 0 xen-dyn-event hvc_console
42: 0 0 0 0 xen-dyn-event vkbd
43: 70 0 0 0 xen-dyn-event vfb
44: 20 0 0 0 xen-dyn-event eth0
NMI: 0 0 0 0 Non-maskable interrupts
LOC: 0 0 0 0 Local timer interrupts
SPU: 0 0 0 0 Spurious interrupts
PMI: 0 0 0 0 Performance monitoring interrupts
IWI: 0 0 0 0 IRQ work interrupts
RTR: 0 0 0 0 APIC ICR read retries
RES: 1872 2411 3713 2474 Rescheduling interrupts
CAL: 206 218 251 219 Function call interrupts
TLB: 0 0 0 0 TLB shootdowns
TRM: 0 0 0 0 Thermal event interrupts
THR: 0 0 0 0 Threshold APIC interrupts
MCE: 0 0 0 0 Machine check exceptions
MCP: 0 0 0 0 Machine check polls
ERR: 0
MIS: 0
00000000-0000ffff : reserved
00010000-0009ffff : System RAM
000a0000-000fffff : reserved
000f0000-000fffff : System ROM
00100000-2007fffff : System RAM
01000000-016549db : Kernel code
016549dc-01ad89ff : Kernel data
01c1a000-01e2afff : Kernel bss
Waiting for init.late [ OK ]
PING build.dumpdata.com (192.168.101.3) 56(84) bytes of data.

--- build.dumpdata.com ping statistics ---
1 packets transmitted, 1 received, 0% packet loss, time 0ms
rtt min/avg/max/mdev = 0.329/0.329/0.329/0.000 ms
NFS done
[0x0->0x100000] pfn
[0x0->0x100000] level entry
[0x100000->0x7cfffff] missing
[0x100000->0x7cfffff] level top
libxl: error: libxl.c:56:libxl_ctx_init Is xenstore daemon running?
failed to stat /var/run/xenstored.pid: No such file or directory
cannot init xl context
[ 4.481012] device-mapper: ioctl: 4.22.0-ioctl (2011-10-19) initialised: dm-devel@xxxxxxxxxx
[ 4.482152] device-mapper: multipath: version 1.3.0 loaded
192.168.101.2:3260,1 iqn.2003-01.org.linux-iscsi.target:sn.726f464255f7b1dc47c8131b3471abeb
192.168.101.2:3260,1 iqn.2003-01.org.linux-iscsi.target:sn.726f464255f7b1dc47c8131b3471abeb
192.168.101.2:3260,1 iqn.2003-01.org.linux-iscsi.target:sn.726f464255f7b1dc47c8131b3471abeb
192.168.101.2:3260,1 iqn.2003-01.org.linux-iscsi.target:sn.726f464255f7b1dc47c8131b3471abeb
192.168.101.2:3260,1 iqn.2003-01.org.linux-iscsi.target:sn.726f464255f7b1dc47c8131b3471abeb
192.168.101.2:3260,1 iqn.2003-01.org.linux-iscsi.target:sn.726f464255f7b1dc47c8131b3471abeb
Logging in to [iface: default, target: iqn.2003-01.org.linux-iscsi.target:sn.726f464255f7b1dc47c8131b3471abeb, portal: 192.168.101.2,3260]
Jan 12 03:21:13 g-pvops iscsid: transport class version 2.0-870. iscsid version 2.0-872
Jan 12 03:21:13 g-pvops iscsid: iSCSI daemon with pid=2387 started!
[ 4.747529] scsi0 : iSCSI Initiator over TCP/IP
[ 4.751948] connection1:0: detected conn error (1020)
iscsiadm: Could not login to [iface: default, target: iqn.2003-01.org.linux-iscsi.target:sn.726f464255f7b1dc47c8131b3471abeb, portal: 192.168.101.2,3260].
iscsiadm: initiator reported error (19 - encountered non-retryable iSCSI login failure)
Jan 12 03:21:14 g-pvops iscsid: conn 0 login rejected: initiator failed authorization with target
Jan 12 03:21:14 g-pvops iscsid: Connection1:0 to [target: iqn.2003-01.org.linux-iscsi.target:sn.726f464255f7b1dc47c8131b3471abeb, portal: 192.168.101.2,3260] through [iface: default] is shutdown.

poweroff
No matching physical volumes found
No volume groups found
Jan 12 03:21:18 g-pvops init: starting pid 2466, tty '/dev/tty2': '/bin/sh'
Jan 12 03:21:18 g-pvops init: starting pid 2469, tty '/dev/tty1': '/bin/sh'
Jan 12 03:21:18 g-pvops init: starting pid 2470, tty '/dev/ttyS0': '/bin/sh'
Jan 12 03:21:18 g-pvops init: starting pid 2471, tty '/dev/hvc0': '/bin/sh'

~~~~~~~~~~~~~~~~~~~~~~~~~~| DirectFB 1.4.9 |~~~~~~~~~~~~~~~~~~~~~~~~~~
(c) 2001-2010 The world wide DirectFB Open Source Community
(c) 2000-2004 Convergence (integrated media) GmbH
----------------------------------------------------------------

(*) DirectFB/Core: Single Application Core. (2012-01-11 18:23)
sh-4.1#
sh-4.1# poweroff
(*) Direct/Memcpy: Using Generic 64bit memcpy()
Jan 12 03:21:18 g-pvops init: starting pid 2477, tty '': '/etc/init.d/halt'
sh-4.1# Usage: /etc/init.d/halt {start}
The system is going down NOW!
Sent SIGTERM to all processes
(!) [ 2465: 0.000] --> Caught signal 15 (sent by pid 1, uid 0) <--
(!) [ 2465: 0.000] --> Caught signal 11 (at 0x38, invalid address) <--
Sent SIGKILL to all processes
Requesting system poweroff
[ 12.086915] System halted.
Parsing config file /mnt/lab/tst018/pv.xm
Daemon running with PID 3972
--
To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
the body of a message to majordomo@xxxxxxxxxxxxxxx
More majordomo info at http://vger.kernel.org/majordomo-info.html
Please read the FAQ at http://www.tux.org/lkml/